Profile of (eval 161)[Text/MicroTemplate.pm:389]

Filename	(eval 161)[/usr/share/perl5/Text/MicroTemplate.pm:389]
Statements	Executed 0 statements in 0s

Subroutines
Calls	P	F	Exclusive Time	Inclusive Time	Subroutine
349	10	7	181ms	181ms	DBI::st::::execute DBI::st::execute (xsub)
4	1	1	87.7ms	206ms	C4::Languages::::getTranslatedLanguages C4::Languages::getTranslatedLanguages
235	235	228	80.2ms	295ms	base::::import base::import (recurses: max depth 3, inclusive time 190ms)
778	2	2	76.7ms	76.7ms	DBI::db::::ping DBI::db::ping (xsub)
289	27	9	75.4ms	2.72s	C4::Context::::preference C4::Context::preference
2714	11	6	52.0ms	56.3ms	List::Util::::first List::Util::first (xsub)
4	2	2	41.6ms	92.4ms	File::Find::::find File::Find::find
520	1	1	36.9ms	40.8ms	File::Spec::Unix::::abs2rel File::Spec::Unix::abs2rel
4582	10	4	27.9ms	27.9ms	Sub::Name::::subname Sub::Name::subname (xsub)
1165	9	6	27.3ms	351ms	Try::Tiny::::try Try::Tiny::try
4513	12	7	19.3ms	19.3ms	next::::method next::method
3453	28	13	17.2ms	17.2ms	UNIVERSAL::::can UNIVERSAL::can (xsub)
1161	1	1	12.9ms	17.8ms	DBD::_::st::::fetchrow_hashref DBD::_::st::fetchrow_hashref (xsub)
58	30	30	12.5ms	13.5ms	B::Hooks::EndOfScope::XS::::__ANON__ B::Hooks::EndOfScope::XS::__ANON__
1207	270	266	11.5ms	11.5ms	warnings::::import warnings::import
644	1	1	10.2ms	10.2ms	DBI::::_new_sth DBI::_new_sth
1226	289	285	9.73ms	9.73ms	strict::::import strict::import
1	1	1	9.44ms	26.6ms	C4::NewsChannels::::GetNewsToDisplay C4::NewsChannels::GetNewsToDisplay
35	8	3	9.42ms	9.43ms	CGI::::param CGI::param
159	159	77	8.74ms	8.74ms	Exporter::::import Exporter::import
2717	10	5	7.57ms	7.57ms	DBI::common::::FETCH DBI::common::FETCH (xsub)
10	2	2	7.55ms	7.55ms	DBI::db::::do DBI::db::do (xsub)
326	2	2	7.06ms	7.28ms	DBD::_::db::::prepare_cached DBD::_::db::prepare_cached
8	1	1	6.61ms	70.1ms	C4::Languages::::getlanguage C4::Languages::getlanguage
238	1	1	6.54ms	6.54ms	XML::SAX::Expat::::_handle_start XML::SAX::Expat::_handle_start
29	29	29	5.98ms	6.74ms	namespace::clean::::import namespace::clean::import
965	39	24	5.12ms	5.12ms	strict::::unimport strict::unimport
1	1	1	4.90ms	14.2ms	DBI::::connect DBI::connect
1547	7	3	4.62ms	4.62ms	DBI::common::::STORE DBI::common::STORE (xsub)
1	1	1	4.55ms	11.2ms	C4::Context::::new C4::Context::new
69	69	13	4.51ms	4.51ms	constant::::import constant::import
764	1	1	4.17ms	4.17ms	XML::SAX::Expat::::_handle_char XML::SAX::Expat::_handle_char
4339	5	4	4.15ms	4.15ms	Scalar::Util::::reftype Scalar::Util::reftype (xsub)
965	7	4	3.99ms	3.99ms	File::Spec::Unix::::canonpath File::Spec::Unix::canonpath (xsub)
326	2	2	3.58ms	10.9ms	DBI::db::::prepare_cached DBI::db::prepare_cached (xsub)
639	3	2	3.32ms	3.32ms	DBI::st::::fetchrow_array DBI::st::fetchrow_array (xsub)
5	3	3	3.23ms	3.51ms	Plack::Sandbox::_2fetc_2fkoha_2fsites_2fkohadev_2fplack_2epsgi::__ANON__
3825	15	9	3.22ms	3.22ms	Scalar::Util::::weaken Scalar::Util::weaken (xsub)
671	6	4	3.08ms	3.08ms	Try::Tiny::::catch Try::Tiny::catch
779	10	6	2.86ms	2.86ms	UNIVERSAL::::isa UNIVERSAL::isa (xsub)
108	4	4	2.74ms	2.74ms	CGI::Util::::rearrange CGI::Util::rearrange
40	1	1	2.61ms	2.75ms	Encode::::decode Encode::decode
8	4	4	2.56ms	2.74ms	Config::::FETCH Config::FETCH
3218	11	8	2.45ms	2.45ms	Scalar::Util::::blessed Scalar::Util::blessed (xsub)
6	6	6	2.41ms	3.50ms	XSLoader::::load XSLoader::load (recurses: max depth 1, inclusive time 232µs)
1163	2	2	2.29ms	2.29ms	DBI::st::::fetch DBI::st::fetch (xsub)
3	1	1	2.18ms	2.18ms	Plack::Middleware::Debug::Environment::__ANON__
238	1	1	2.01ms	2.01ms	XML::SAX::Expat::::_handle_end XML::SAX::Expat::_handle_end
1280	17	3	1.90ms	1.90ms	DBI::common::::DESTROY DBI::common::DESTROY (xsub)
688	3	3	1.85ms	1.85ms	mro::::get_linear_isa mro::get_linear_isa (xsub)
3	1	1	1.84ms	5.13ms	Plack::Component::::__ANON__[:72] Plack::Component::__ANON__[:72]
2	2	2	1.71ms	1.71ms	DynaLoader::::bootstrap DynaLoader::bootstrap
1525	8	1	1.57ms	1.65ms	Package::Stash::XS::::namespace Package::Stash::XS::namespace (xsub)
1161	1	1	1.56ms	1.56ms	DBI::st::::mysql_async_ready DBI::st::mysql_async_ready (xsub)
319	1	1	1.26ms	1.26ms	DBI::st::::bind_param DBI::st::bind_param (xsub)
990	3	1	1.25ms	1.25ms	DBI::common::::func DBI::common::func (xsub)
4	4	3	1.23ms	1.23ms	CGI::::AUTOLOAD CGI::AUTOLOAD
8	8	8	1.15ms	1.15ms	Modern::Perl::::import Modern::Perl::import
1	1	1	1.11ms	1.47ms	PerlIO::::import PerlIO::import
2	2	1	974µs	1.95ms	Module::Runtime::::require_module Module::Runtime::require_module
174	174	174	949µs	949µs	utf8::::import utf8::import
6	1	1	892µs	8.22ms	DBD::_::st::::bind_columns DBD::_::st::bind_columns
9	1	1	858µs	858µs	YAML::Syck::::Load YAML::Syck::Load
37	11	5	798µs	14.7ms	C4::Context::::dbh C4::Context::dbh
204	2	1	790µs	790µs	CGI::Util::::unescape CGI::Util::unescape
314	3	2	752µs	5.21ms	DBI::st::::fetchrow_hashref DBI::st::fetchrow_hashref (xsub)
5	2	1	750µs	816µs	C4::Context::::set_userenv C4::Context::set_userenv
4	1	1	750µs	8.16ms	DBD::_::st::::fetchall_arrayref DBD::_::st::fetchall_arrayref
4	1	1	723µs	9.64ms	C4::Members::::GetMember C4::Members::GetMember
50	50	39	709µs	709µs	warnings::::unimport warnings::unimport
15	1	1	676µs	700µs	Encode::::encode Encode::encode
13	13	12	624µs	624µs	vars::::import vars::import
640	17	3	623µs	623µs	DBD::_mem::common::::DESTROY DBD::_mem::common::DESTROY (xsub)
518	2	2	620µs	620µs	File::Spec::Unix::::splitdir File::Spec::Unix::splitdir
4	1	1	607µs	607µs	C4::Languages::::regex_lang_subtags C4::Languages::regex_lang_subtags
9	1	1	564µs	564µs	YAML::Syck::::Dump YAML::Syck::Dump
325	3	3	491µs	491µs	DBI::st::::finish DBI::st::finish (xsub)
5	3	3	402µs	402µs	File::pushd::::pushd File::pushd::pushd
37	2	2	391µs	628µs	File::Spec::Unix::::catfile File::Spec::Unix::catfile (xsub)
7	7	7	343µs	343µs	CGI::::import CGI::import
9	9	9	328µs	328µs	overload::::import overload::import
520	1	1	323µs	323µs	File::Spec::Unix::::curdir File::Spec::Unix::curdir
66	2	1	273µs	273µs	CGI::Util::::escape CGI::Util::escape
1	1	1	254µs	284µs	POSIX::strftime::Compiler::::strftime POSIX::strftime::Compiler::strftime
339	1	1	249µs	249µs	DBD::_::st::::bind_col DBD::_::st::bind_col (xsub)
189	10	1	240µs	240µs	Plack::Util::Accessor::::__ANON__ Plack::Util::Accessor::__ANON__
63	4	3	234µs	274µs	File::Spec::Unix::::catdir File::Spec::Unix::catdir (xsub)
71	6	4	229µs	229µs	C4::Context::::userenv C4::Context::userenv
57	5	5	218µs	218µs	CGI::::self_or_default CGI::self_or_default
90	1	1	208µs	208µs	Encode::Encoding::::renewed Encode::Encoding::renewed
5	3	3	205µs	205µs	CGI::::initialize_globals CGI::initialize_globals
21	8	3	196µs	196µs	C4::Context::::config C4::Context::config
40	1	1	186µs	186µs	File::Spec::Unix::file_name_is_absolute
1	1	1	178µs	178µs	Class::Accessor::::mk_accessors Class::Accessor::mk_accessors
16	7	5	164µs	164µs	version::vxs::::_VERSION version::vxs::_VERSION (xsub)
108	5	4	162µs	162µs	DBI::st::::fetchrow DBI::st::fetchrow (xsub)
1	1	1	159µs	37.6ms	Koha::Objects::::next Koha::Objects::next
4	1	1	158µs	158µs	Exporter::::export_to_level Exporter::export_to_level
5	1	1	153µs	153µs	Plack::Component::::to_app_auto Plack::Component::to_app_auto
1	1	1	150µs	150µs	XML::LibXML::::import XML::LibXML::import
5	1	1	132µs	132µs	File::pushd::::DESTROY File::pushd::DESTROY
32	1	1	122µs	122µs	XML::SAX::Expat::::_handle_comment XML::SAX::Expat::_handle_comment
9	9	9	121µs	121µs	List::Util::::import List::Util::import
23	8	5	118µs	1.01ms	DBI::db::::prepare DBI::db::prepare (xsub)
4	1	1	109µs	109µs	CGI::Util::::expires CGI::Util::expires
40	1	1	101µs	101µs	Encode::::is_utf8 Encode::is_utf8 (xsub)
5	5	1	100µs	100µs	DBD::_::common::::install_method DBD::_::common::install_method
4	1	1	95µs	95µs	IO::Handle::::read IO::Handle::read
42	5	3	87µs	87µs	Text::MicroTemplate::EncodedString::__ANON__
114	4	1	80µs	80µs	Package::Stash::XS::::name Package::Stash::XS::name (xsub)
1	1	1	79µs	79µs	Sub::Exporter::Progressive::::import Sub::Exporter::Progressive::import
8	2	1	77µs	77µs	C4::Templates::::theme C4::Templates::theme
1	1	1	73µs	462µs	Koha::Objects::::search Koha::Objects::search
7	2	2	70µs	70µs	SelectSaver::::DESTROY SelectSaver::DESTROY
1	1	1	68µs	0s	DateTime::TimeZone::::new DateTime::TimeZone::new (recurses: max depth 1, inclusive time 68µs)
12	1	1	66µs	66µs	DateTime::::__ANON__ DateTime::__ANON__
2	1	1	62µs	62µs	File::Basename::::basename File::Basename::basename
1	1	1	59µs	59µs	POSIX::::import POSIX::import
8	1	1	58µs	58µs	List::MoreUtils::::uniq List::MoreUtils::uniq (xsub)
108	8	1	56µs	56µs	Plack::Component::::CORE:subst Plack::Component::CORE:subst (opcode)
8	2	1	55µs	55µs	C4::Templates::::interface C4::Templates::interface
4	4	4	55µs	55µs	Config::::import Config::import
1	1	1	54µs	54µs	Encode::utf8::::encode_xs Encode::utf8::encode_xs (xsub)
14	14	14	53µs	53µs	C4::Context::::import C4::Context::import
18	2	1	53µs	53µs	Text::MicroTemplate::::encoded_string Text::MicroTemplate::encoded_string
12	1	1	52µs	52µs	Tie::Hash::NamedCapture::::FETCH Tie::Hash::NamedCapture::FETCH (xsub)
8	2	1	50µs	50µs	C4::Templates::::filename C4::Templates::filename
2	1	1	45µs	45µs	DateTime::::_stringify DateTime::_stringify
3	2	1	45µs	45µs	Module::Runtime::module_notional_filename
3	3	3	45µs	45µs	Module::Runtime::::import Module::Runtime::import
4	1	1	44µs	44µs	CGI::::self_or_CGI CGI::self_or_CGI
1	1	1	41µs	41µs	DBI::::_new_drh DBI::_new_drh
12	3	1	39µs	39µs	C4::Context::::set_shelves_userenv C4::Context::set_shelves_userenv
2	1	1	39µs	39µs	XML::Parser::Expat::::DESTROY XML::Parser::Expat::DESTROY
12	3	1	37µs	37µs	C4::Templates::::lang C4::Templates::lang
1	1	1	37µs	37µs	Module::Runtime::use_package_optimistically
1	1	1	34µs	34µs	parent::::import parent::import
4	1	1	33µs	33µs	C4::Context::::interface C4::Context::interface
6	6	6	32µs	32µs	mro::::import mro::import
6	1	1	31µs	31µs	Apache::LogFormat::Compiler::::_safe Apache::LogFormat::Compiler::_safe
5	2	1	31µs	31µs	C4::Context::::_new_userenv C4::Context::_new_userenv
5	1	1	30µs	30µs	CGI::::charset CGI::charset
1	1	1	30µs	30µs	POSIX::::strftime POSIX::strftime (xsub)
8	2	1	28µs	28µs	C4::Templates::::preferredtheme C4::Templates::preferredtheme
2	2	2	28µs	28µs	Module::Runtime::::use_module Module::Runtime::use_module
1	1	1	27µs	27µs	DBI::::_new_dbh DBI::_new_dbh
2	2	2	22µs	22µs	Sub::Exporter::Progressive::::__ANON__ Sub::Exporter::Progressive::__ANON__
15	1	1	22µs	22µs	Encode::::FB_XMLCREF Encode::FB_XMLCREF (xsub)
6	1	1	21µs	21µs	Apache::LogFormat::Compiler::::_string Apache::LogFormat::Compiler::_string
5	2	1	21µs	21µs	Koha::::version Koha::version
1	1	1	20µs	20µs	Encode::::find_encoding Encode::find_encoding
4	1	1	20µs	20µs	C4::Templates::::activethemes C4::Templates::activethemes
4	1	1	19µs	19µs	C4::Templates::::htdocs C4::Templates::htdocs
4	4	3	15µs	15µs	Class::Accessor::::import Class::Accessor::import
1	1	1	15µs	15µs	Encode::Encoding::::renew Encode::Encoding::renew
5	2	2	15µs	15µs	mro::::set_mro mro::set_mro (xsub)
1	1	1	13µs	13µs	Koha::Database::::schema Koha::Database::schema
1	1	1	11µs	1.12ms	DBI::db::::get_info DBI::db::get_info (xsub)
2	1	1	11µs	919µs	DBI::st::::bind_columns DBI::st::bind_columns (xsub)
1	1	1	11µs	11µs	File::Spec::Unix::::splitpath File::Spec::Unix::splitpath
1	1	1	8µs	8µs	Class::Accessor::::new Class::Accessor::new
1	1	1	7µs	7µs	if::::import if::import
2	2	2	7µs	7µs	Encode::::PERLQQ Encode::PERLQQ (xsub)
3	1	1	7µs	7µs	overload::::AddrRef overload::AddrRef
1	1	1	7µs	7µs	bytes::::import bytes::import
3	2	2	4µs	4µs	Scalar::Util::::refaddr Scalar::Util::refaddr (xsub)
1	1	1	1µs	1µs	Encode::Encoding::::needs_lines Encode::Encoding::needs_lines
1	1	1	1µs	1µs	Internals::::SvREADONLY Internals::SvREADONLY (xsub)
1	1	1	500ns	500ns	Encode::::STOP_AT_PARTIAL Encode::STOP_AT_PARTIAL (xsub)
1	1	1	500ns	500ns	Encode::::WARN_ON_ERR Encode::WARN_ON_ERR (xsub)
0	0	0	0s	0s	Plack::Component::::__ANON__[:3] Plack::Component::__ANON__[:3]
0	0	0	0s	0s	Plack::Component::::__ANON__[:74] Plack::Component::__ANON__[:74]

Call graph for these subroutines as a Graphviz dot language file.

Line	Calls	Time in subs	Code
1			package Plack::Component;
2			sub {
3			local $SIG{__WARN__} = sub { print STDERR $_mt->_error(shift, 4, $_from) };
4			Text::MicroTemplate::encoded_string((
5			# spent 5.13ms (1.84+3.30) within Plack::Component::__ANON__[(eval 161)[/usr/share/perl5/Text/MicroTemplate.pm:389]:72] which was called 3 times, avg 1.71ms/call: # 3 times (1.84ms+3.30ms) by Plack::Component::__ANON__[(eval 161)[/usr/share/perl5/Text/MicroTemplate.pm:389]:74] at line 73, avg 1.71ms/call sub { my $_MT = ''; local $Plack::Component::_MTREF = \$_MT; my $_MT_T = '';my $stash = $_[0];
6			;
7
- -
11	3	8µs	$_MT .="\<script\ type\=\"text\/javascript\"\ charset\=\"utf\-8\"\>\n\ \ \ \ \/\/\ When\ jQuery\ is\ sourced\,\ it\'s\ going\ to\ overwrite\ whatever\ might\ be\ in\ the\n\ \ \ \ \/\/\ \'\$\'\ variable\,\ so\ store\ a\ reference\ of\ it\ in\ a\ temporary\ variable\.\.\.\n\ \ \ \ var\ _\$\ \=\ window\.\$\;\n\ \ \ \ if\ $typeof\ jQuery\ \=\=\ \'undefined\'$\ \{\n\ \ \ \ \ \ \ \ var\ jquery_url\ \=\ \'";$_MT_T = $stash->{BASE_URL} ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = ''; # spent 8µs making 3 calls to Plack::Component::CORE:subst, avg 3µs/call
12
- -
15	3	800ns	$_MT .="\/debug_toolbar\/jquery\.js\'\;\n\ \ \ \ \ \ \ \ document\.write$unescape\(\'\%3Cscript\ src\=\"\'\ \+\ jquery_url\ \+\ \'\"\ type\=\"text\/javascript\"\%3E\%3C\/script\%3E\'$\)\;\n\ \ \ \ \}\n\<\/script\>\n\<script\ type\=\"text\/javascript\"\ src\=\"";$_MT_T = $stash->{BASE_URL} ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = ''; # spent 800ns making 3 calls to Plack::Component::CORE:subst, avg 267ns/call
16
- -
21	3	500ns	$_MT .="\/debug_toolbar\/toolbar\.min\.js\"\>\<\/script\>\n\<script\ type\=\"text\/javascript\"\ charset\=\"utf\-8\"\>\n\ \ \ \ \/\/\ Now\ that\ jQuery\ is\ done\ loading\,\ put\ the\ \'\$\'\ variable\ back\ to\ what\ it\ was\.\.\.\n\ \ \ \ var\ \$\ \=\ _\$\;\n\<\/script\>\n\<style\ type\=\"text\/css\"\>\n\ \ \ \ \@import\ url\(";$_MT_T = $stash->{BASE_URL} ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = ''; # spent 500ns making 3 calls to Plack::Component::CORE:subst, avg 167ns/call
22
- -
25			$_MT .="\/debug_toolbar\/toolbar\.min\.css\)\;\n\<\/style\>\n\<div\ id\=\"plDebug\"\>\n\ \ \ \ \<div\ style\=\"display\:none\;\"\ id\=\"plDebugToolbar\"\>\n\ \ \ \ \ \ \ \ \<ul\ id\=\"plDebugPanelList\"\>\n";
26			if ($stash->{panels}) {
27			;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \<li\>\<a\ id\=\"plHideToolBarButton\"\ href\=\"\#\"\ title\=\"Hide\ Toolbar\"\>Hide\ \&raquo\;\<\/a\>\<\/li\>\n";
28			} else {
29			;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \<li\ id\=\"plDebugButton\"\>DEBUG\<\/li\>\n";
30			}
31			for my $panel (reverse @{$stash->{panels}}) {
32			;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<li\>\n";
33	24	42µs	if ($panel->content) { # spent 24µs making 9 calls to Text::MicroTemplate::EncodedString::__ANON__, avg 3µs/call # spent 18µs making 15 calls to Plack::Util::Accessor::__ANON__, avg 1µs/call
34	90	105µs	;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<a\ href\=\"";$_MT_T = $panel->url ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = '';$_MT .="\"\ title\=\"";$_MT_T = $panel->title ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = '';$_MT .="\"\ class\=\"";$_MT_T = $panel->dom_id ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = '';$_MT .="\"\>\n"; # spent 83µs making 45 calls to Plack::Util::Accessor::__ANON__, avg 2µs/call # spent 22µs making 45 calls to Plack::Component::CORE:subst, avg 480ns/call
35			} else {
36			;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<div\ class\=\"contentless\"\>\n";
37			}
38	30	25µs	;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ ";$_MT_T = $panel->nav_title ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = '';$_MT .="\n"; # spent 20µs making 15 calls to Plack::Util::Accessor::__ANON__, avg 1µs/call # spent 5µs making 15 calls to Plack::Component::CORE:subst, avg 333ns/call
39	15	16µs	if ($panel->nav_subtitle) { # spent 16µs making 15 calls to Plack::Util::Accessor::__ANON__, avg 1µs/call
40	18	12µs	;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<br\>\<small\>";$_MT_T = $panel->nav_subtitle ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = '';$_MT .="\<\/small\>\n"; # spent 8µs making 9 calls to Plack::Util::Accessor::__ANON__, avg 933ns/call # spent 4µs making 9 calls to Plack::Component::CORE:subst, avg 400ns/call
41			}
42	24	27µs	if ($panel->content) { # spent 14µs making 9 calls to Text::MicroTemplate::EncodedString::__ANON__, avg 2µs/call # spent 13µs making 15 calls to Plack::Util::Accessor::__ANON__, avg 873ns/call
43			;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<\/a\>\n";
44			} else {
45			;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<\/div\>\n";
46			}
47			;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<\/li\>\n";
48			} # end for
49			;
50
- -
53			$_MT .="\ \ \ \ \ \ \ \ \<\/ul\>\n\ \ \ \ \<\/div\>\n\ \ \ \ \<div\ style\=\"display\:none\;\"\ id\=\"plDebugToolbarHandle\"\>\n\ \ \ \ \ \ \ \ \<a\ title\=\"Show\ Toolbar\"\ id\=\"plShowToolBarButton\"\ href\=\"\#\"\>\&laquo\;\<\/a\>\n\ \ \ \ \<\/div\>\n";
54			for my $panel (reverse @{$stash->{panels}}) {
55	24	36µs	if ($panel->content) { # spent 22µs making 15 calls to Plack::Util::Accessor::__ANON__, avg 1µs/call # spent 14µs making 9 calls to Text::MicroTemplate::EncodedString::__ANON__, avg 2µs/call
56	30	26µs	;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \<div\ id\=\"";$_MT_T = $panel->dom_id ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = ''; # spent 15µs making 15 calls to Plack::Util::Accessor::__ANON__, avg 1µs/call # spent 11µs making 15 calls to Plack::Component::CORE:subst, avg 740ns/call
57
58
59	30	25µs	$_MT .="\"\ class\=\"panelContent\"\>\n\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<div\ class\=\"plDebugPanelTitle\"\>\n\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<a\ href\=\"\"\ class\=\"plDebugClose\"\>Close\<\/a\>\n\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<h3\>";$_MT_T = $panel->title ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = ''; # spent 19µs making 15 calls to Plack::Util::Accessor::__ANON__, avg 1µs/call # spent 5µs making 15 calls to Plack::Component::CORE:subst, avg 353ns/call
60
61
62			$_MT .="\<\/h3\>\n\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<\/div\>\n\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<div\ class\=\"plDebugPanelContent\"\>\n\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<div\ class\=\"scroll\"\>\n";
63	33	2.20ms	my $content = ref $panel->content eq 'CODE' ? $panel->content->() : $panel->content; # spent 2.18ms making 3 calls to Plack::Middleware::Debug::Environment::__ANON__, avg 727µs/call # spent 25µs making 30 calls to Plack::Util::Accessor::__ANON__, avg 837ns/call
64	30	722µs	$content = Encode::encode('latin1', $content, Encode::FB_XMLCREF); # spent 700µs making 15 calls to Encode::encode, avg 47µs/call # spent 22µs making 15 calls to Encode::FB_XMLCREF, avg 1µs/call
65	15	45µs	;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ ";$_MT_T = Text::MicroTemplate::encoded_string($content) ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = ''; # spent 45µs making 15 calls to Text::MicroTemplate::encoded_string, avg 3µs/call
66
67
68			$_MT .="\n\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<\/div\>\n\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<\/div\>\n\ \ \ \ \ \ \ \ \ \ \ \ \<\/div\>\n";
69			}
70			} # end for
71			;
72			$_MT .="\ \ \ \ \<div\ id\=\"plDebugWindow\"\ class\=\"panelContent\"\>\<\/div\>\n\<\/div\>\n";return $_MT; }
73	6	5.14ms	)->(@_)); # spent 5.13ms making 3 calls to Plack::Component::__ANON__[(eval 161)[Text/MicroTemplate.pm:389]:72], avg 1.71ms/call # spent 8µs making 3 calls to Text::MicroTemplate::encoded_string, avg 3µs/call
74			}
75
76			;

			# spent 249µs within DBD::_::st::bind_col which was called 339 times, avg 735ns/call: # 339 times (249µs+0s) by DBD::mysql::st::__ANON__[/usr/lib/x86_64-linux-gnu/perl5/5.20/DBD/mysql.pm:810] at line 809 of DBD/mysql.pm, avg 735ns/call sub DBD::_::st::bind_col; # xsub
			# spent 17.8ms (12.9+4.90) within DBD::_::st::fetchrow_hashref which was called 1161 times, avg 15µs/call: # 1161 times (12.9ms+4.90ms) by DBD::mysql::st::__ANON__[/usr/lib/x86_64-linux-gnu/perl5/5.20/DBD/mysql.pm:799] at line 798 of DBD/mysql.pm, avg 15µs/call sub DBD::_::st::fetchrow_hashref; # xsub
			# spent 623µs within DBD::_mem::common::DESTROY which was called 640 times, avg 973ns/call: # 200 times (170µs+0s) by C4::Languages::getTranslatedLanguages at line 390 of C4/Languages.pm, avg 851ns/call # 84 times (97µs+0s) by C4::Languages::getTranslatedLanguages at line 348 of C4/Languages.pm, avg 1µs/call # 84 times (76µs+0s) by C4::Languages::getTranslatedLanguages at line 350 of C4/Languages.pm, avg 910ns/call # 84 times (67µs+0s) by C4::Languages::getTranslatedLanguages at line 351 of C4/Languages.pm, avg 793ns/call # 84 times (65µs+0s) by C4::Languages::getTranslatedLanguages at line 349 of C4/Languages.pm, avg 776ns/call # 76 times (92µs+0s) by C4::Languages::getTranslatedLanguages at line 364 of C4/Languages.pm, avg 1µs/call # 5 times (9µs+0s) by C4::Auth::get_user_subpermissions at line 1881 of C4/Auth.pm, avg 2µs/call # 5 times (8µs+0s) by C4::Auth::getuserflags at line 1976 of C4/Auth.pm, avg 2µs/call # 4 times (17µs+0s) by C4::Members::GetMember at line 224 of C4/Auth.pm, avg 4µs/call # 4 times (8µs+0s) by C4::Auth::get_all_subpermissions at line 253 of C4/Auth.pm, avg 2µs/call # 4 times (3µs+0s) by C4::Auth::haspermission at line 890 of C4/Auth.pm, avg 750ns/call # once (4µs+0s) by C4::NewsChannels::GetNewsToDisplay at line 50 of mainpage.pl # once (2µs+0s) by C4::Review::numberofreviews at line 65 of mainpage.pl # once (2µs+0s) by C4::Suggestions::CountSuggestion at line 67 of mainpage.pl # once (1µs+0s) by Koha::Borrower::Modifications::GetPendingModificationsCount at line 68 of mainpage.pl # once (1µs+0s) by C4::Tags::get_count_by_tag_status at line 66 of mainpage.pl # once (900ns+0s) by C4::Auth::haspermission at line 1668 of C4/Auth.pm sub DBD::_mem::common::DESTROY; # xsub
			# spent 1.90ms within DBI::common::DESTROY which was called 1280 times, avg 1µs/call: # 400 times (590µs+0s) by C4::Languages::getTranslatedLanguages at line 390 of C4/Languages.pm, avg 1µs/call # 168 times (263µs+0s) by C4::Languages::getTranslatedLanguages at line 348 of C4/Languages.pm, avg 2µs/call # 168 times (236µs+0s) by C4::Languages::getTranslatedLanguages at line 351 of C4/Languages.pm, avg 1µs/call # 168 times (227µs+0s) by C4::Languages::getTranslatedLanguages at line 350 of C4/Languages.pm, avg 1µs/call # 168 times (214µs+0s) by C4::Languages::getTranslatedLanguages at line 349 of C4/Languages.pm, avg 1µs/call # 152 times (231µs+0s) by C4::Languages::getTranslatedLanguages at line 364 of C4/Languages.pm, avg 2µs/call # 10 times (18µs+0s) by C4::Auth::get_user_subpermissions at line 1881 of C4/Auth.pm, avg 2µs/call # 10 times (14µs+0s) by C4::Auth::getuserflags at line 1976 of C4/Auth.pm, avg 1µs/call # 8 times (40µs+0s) by C4::Members::GetMember at line 224 of C4/Auth.pm, avg 5µs/call # 8 times (17µs+0s) by C4::Auth::get_all_subpermissions at line 253 of C4/Auth.pm, avg 2µs/call # 8 times (14µs+0s) by C4::Auth::haspermission at line 890 of C4/Auth.pm, avg 2µs/call # 2 times (10µs+0s) by C4::NewsChannels::GetNewsToDisplay at line 50 of mainpage.pl, avg 5µs/call # 2 times (6µs+0s) by C4::Suggestions::CountSuggestion at line 67 of mainpage.pl, avg 3µs/call # 2 times (6µs+0s) by C4::Review::numberofreviews at line 65 of mainpage.pl, avg 3µs/call # 2 times (5µs+0s) by C4::Auth::haspermission at line 1668 of C4/Auth.pm, avg 2µs/call # 2 times (4µs+0s) by C4::Tags::get_count_by_tag_status at line 66 of mainpage.pl, avg 2µs/call # 2 times (4µs+0s) by Koha::Borrower::Modifications::GetPendingModificationsCount at line 68 of mainpage.pl, avg 2µs/call sub DBI::common::DESTROY; # xsub
			# spent 7.57ms within DBI::common::FETCH which was called 2717 times, avg 3µs/call: # 1161 times (2.62ms+0s) by DBD::_::st::fetchrow_hashref at line 798 of DBD/mysql.pm, avg 2µs/call # 769 times (3.77ms+0s) by DBIx::Class::Storage::DBI::_seems_connected at line 937 of DBIx/Class/Storage/DBI.pm, avg 5µs/call # 769 times (1.09ms+0s) by DBIx::Class::Storage::DBI::connected at line 929 of DBIx/Class/Storage/DBI.pm, avg 1µs/call # 9 times (42µs+0s) by CGI::Session::Driver::DBI::DESTROY at line 141 of CGI/Session/Driver/DBI.pm, avg 5µs/call # 2 times (22µs+0s) by DBIx::Class::Storage::DBI::Cursor::next at line 127 of DBIx/Class/Storage/DBI/Cursor.pm, avg 11µs/call # 2 times (7µs+0s) by Try::Tiny::try at line 252 of DBIx/Class/Storage/DBI/Cursor.pm, avg 4µs/call # 2 times (6µs+0s) by DBIx::Class::Storage::DBI::_determine_driver at line 1255 of DBIx/Class/Storage/DBI.pm, avg 3µs/call # once (12µs+0s) by DBIx::Class::Storage::DBI::mysql::_run_connection_actions at line 94 of DBIx/Class/Storage/DBI/mysql.pm # once (4µs+0s) by Try::Tiny::try at line 1492 of DBIx/Class/Storage/DBI.pm # once (0s+0s) by DBIx::Class::Storage::DBI::_connect at line 1531 of DBIx/Class/Storage/DBI.pm sub DBI::common::FETCH; # xsub
			# spent 4.62ms within DBI::common::STORE which was called 1547 times, avg 3µs/call: # 769 times (2.70ms+0s) by DBIx::Class::Storage::DBI::connected at line 945 of DBIx/Class/Storage/DBI.pm, avg 4µs/call # 769 times (1.89ms+0s) by DBIx::Class::Storage::DBI::connected at line 929 of DBIx/Class/Storage/DBI.pm, avg 2µs/call # 3 times (13µs+0s) by DBI::connect at line 723 of DBI.pm, avg 4µs/call # 3 times (5µs+0s) by DBI::connect at line 726 of DBI.pm, avg 2µs/call # once (6µs+0s) by C4::Context::preference at line 91 of Koha/Database.pm # once (5µs+0s) by DBI::connect at line 742 of DBI.pm # once (4µs+0s) by C4::Context::preference at line 95 of Koha/Database.pm sub DBI::common::STORE; # xsub
			# spent 1.25ms within DBI::common::func which was called 990 times, avg 1µs/call: # 644 times (904µs+0s) by DBD::mysql::db::prepare at line 232 of DBD/mysql.pm, avg 1µs/call # 345 times (338µs+0s) by DBD::mysql::st::__ANON__[/usr/lib/x86_64-linux-gnu/perl5/5.20/DBD/mysql.pm:810] at line 808 of DBD/mysql.pm, avg 981ns/call # once (4µs+0s) by DBD::mysql::db::get_info at line 759 of DBD/mysql.pm sub DBI::common::func; # xsub
			# spent 7.55ms within DBI::db::do which was called 10 times, avg 755µs/call: # 9 times (7.41ms+0s) by CGI::Session::Driver::mysql::store at line 50 of CGI/Session/Driver/mysql.pm, avg 824µs/call # once (137µs+0s) by DBIx::Class::Storage::DBI::__ANON__[/usr/share/perl5/DBIx/Class/Storage/DBI.pm:1440] at line 1438 of DBIx/Class/Storage/DBI.pm sub DBI::db::do; # xsub
			# spent 1.12ms (11µs+1.11) within DBI::db::get_info which was called: # once (11µs+1.11ms) by DBIx::Class::Storage::DBI::_dbh_get_info at line 1170 of DBIx/Class/Storage/DBI.pm sub DBI::db::get_info; # xsub
			# spent 76.7ms within DBI::db::ping which was called 778 times, avg 99µs/call: # 769 times (76.5ms+0s) by DBIx::Class::Storage::DBI::_ping at line 941 of DBIx/Class/Storage/DBI.pm, avg 99µs/call # 9 times (232µs+0s) by CGI::Session::Driver::DBI::DESTROY at line 136 of CGI/Session/Driver/DBI.pm, avg 26µs/call sub DBI::db::ping; # xsub
			# spent 1.01ms (118µs+891µs) within DBI::db::prepare which was called 23 times, avg 44µs/call: # 5 times (24µs+262µs) by C4::Auth::haspermission at line 1973 of C4/Auth.pm, avg 57µs/call # 5 times (27µs+144µs) by C4::Auth::getuserflags at line 1868 of C4/Auth.pm, avg 34µs/call # 5 times (17µs+140µs) by C4::Auth::get_user_subpermissions at line 1919 of C4/Auth.pm, avg 31µs/call # 4 times (23µs+196µs) by C4::Auth::get_all_subpermissions at line 1948 of C4/Auth.pm, avg 55µs/call # once (6µs+49µs) by C4::Review::numberofreviews at line 123 of C4/Review.pm # once (6µs+45µs) by C4::Suggestions::CountSuggestion at line 417 of C4/Suggestions.pm # once (13µs+27µs) by Koha::Borrower::Modifications::GetPendingModificationsCount at line 122 of Koha/Borrower/Modifications.pm # once (5µs+27µs) by C4::Tags::get_count_by_tag_status at line 120 of C4/Tags.pm sub DBI::db::prepare; # xsub
			# spent 10.9ms (3.58+7.28) within DBI::db::prepare_cached which was called 326 times, avg 33µs/call: # 317 times (3.50ms+7.08ms) by DBIx::Class::Storage::DBI::_prepare_sth at line 1846 of DBIx/Class/Storage/DBI.pm, avg 33µs/call # 9 times (73µs+207µs) by CGI::Session::Driver::DBI::retrieve at line 68 of CGI/Session/Driver/DBI.pm, avg 31µs/call sub DBI::db::prepare_cached; # xsub
			# spent 919µs (11+908) within DBI::st::bind_columns which was called 2 times, avg 459µs/call: # 2 times (11µs+908µs) by DBIx::Class::Storage::DBI::Cursor::next at line 128 of DBIx/Class/Storage/DBI/Cursor.pm, avg 459µs/call sub DBI::st::bind_columns; # xsub
			# spent 1.26ms within DBI::st::bind_param which was called 319 times, avg 4µs/call: # 319 times (1.26ms+0s) by DBIx::Class::Storage::DBI::_bind_sth_params at line 1887 of DBIx/Class/Storage/DBI.pm, avg 4µs/call sub DBI::st::bind_param; # xsub
			# spent 181ms within DBI::st::execute which was called 349 times, avg 518µs/call: # 317 times (178ms+0s) by DBIx::Class::Storage::DBI::_dbh_execute at line 1832 of DBIx/Class/Storage/DBI.pm, avg 562µs/call # 9 times (1.12ms+0s) by CGI::Session::Driver::DBI::retrieve at line 72 of CGI/Session/Driver/DBI.pm, avg 125µs/call # 5 times (458µs+0s) by C4::Auth::get_user_subpermissions at line 1925 of C4/Auth.pm, avg 92µs/call # 5 times (237µs+0s) by C4::Auth::getuserflags at line 1869 of C4/Auth.pm, avg 47µs/call # 5 times (223µs+0s) by C4::Auth::haspermission at line 1974 of C4/Auth.pm, avg 45µs/call # 4 times (271µs+0s) by C4::Auth::get_all_subpermissions at line 1951 of C4/Auth.pm, avg 68µs/call # once (71µs+0s) by C4::Review::numberofreviews at line 124 of C4/Review.pm # once (42µs+0s) by C4::Suggestions::CountSuggestion at line 418 of C4/Suggestions.pm # once (37µs+0s) by C4::Tags::get_count_by_tag_status at line 121 of C4/Tags.pm # once (36µs+0s) by Koha::Borrower::Modifications::GetPendingModificationsCount at line 123 of Koha/Borrower/Modifications.pm sub DBI::st::execute; # xsub
			# spent 2.29ms within DBI::st::fetch which was called 1163 times, avg 2µs/call: # 1161 times (2.28ms+0s) by DBD::_::st::fetchrow_hashref at line 798 of DBD/mysql.pm, avg 2µs/call # 2 times (14µs+0s) by DBIx::Class::Storage::DBI::Cursor::next at line 137 of DBIx/Class/Storage/DBI/Cursor.pm, avg 7µs/call sub DBI::st::fetch; # xsub
			# spent 162µs within DBI::st::fetchrow which was called 108 times, avg 1µs/call: # 100 times (132µs+0s) by C4::Auth::getuserflags at line 1871 of C4/Auth.pm, avg 1µs/call # 5 times (20µs+0s) by C4::Auth::haspermission at line 1975 of C4/Auth.pm, avg 4µs/call # once (4µs+0s) by C4::Review::numberofreviews at line 125 of C4/Review.pm # once (3µs+0s) by C4::Suggestions::CountSuggestion at line 420 of C4/Suggestions.pm # once (3µs+0s) by C4::Tags::get_count_by_tag_status at line 122 of C4/Tags.pm sub DBI::st::fetchrow; # xsub
			# spent 3.32ms within DBI::st::fetchrow_array which was called 639 times, avg 5µs/call: # 315 times (2.35ms+0s) by DBIx::Class::Storage::DBI::select_single at line 2565 of DBIx/Class/Storage/DBI.pm, avg 7µs/call # 315 times (924µs+0s) by DBIx::Class::Storage::DBI::select_single at line 2566 of DBIx/Class/Storage/DBI.pm, avg 3µs/call # 9 times (47µs+0s) by CGI::Session::Driver::DBI::retrieve at line 74 of CGI/Session/Driver/DBI.pm, avg 5µs/call sub DBI::st::fetchrow_array; # xsub
			# spent 5.21ms (752µs+4.45) within DBI::st::fetchrow_hashref which was called 314 times, avg 17µs/call: # 308 times (721µs+4.27ms) by C4::Auth::get_all_subpermissions at line 1954 of C4/Auth.pm, avg 16µs/call # 5 times (26µs+155µs) by C4::Auth::get_user_subpermissions at line 1928 of C4/Auth.pm, avg 36µs/call # once (6µs+30µs) by Koha::Borrower::Modifications::GetPendingModificationsCount at line 124 of Koha/Borrower/Modifications.pm sub DBI::st::fetchrow_hashref; # xsub
			# spent 491µs within DBI::st::finish which was called 325 times, avg 2µs/call: # 315 times (467µs+0s) by DBIx::Class::Storage::DBI::select_single at line 2571 of DBIx/Class/Storage/DBI.pm, avg 1µs/call # 9 times (20µs+0s) by CGI::Session::Driver::DBI::retrieve at line 76 of CGI/Session/Driver/DBI.pm, avg 2µs/call # once (3µs+0s) by Try::Tiny::try at line 251 of DBIx/Class/Storage/DBI/Cursor.pm sub DBI::st::finish; # xsub
			# spent 1.56ms within DBI::st::mysql_async_ready which was called 1161 times, avg 1µs/call: # 1161 times (1.56ms+0s) by DBD::mysql::st::__ANON__[/usr/lib/x86_64-linux-gnu/perl5/5.20/DBD/mysql.pm:799] at line 795 of DBD/mysql.pm, avg 1µs/call sub DBI::st::mysql_async_ready; # xsub
			# spent 22µs within Encode::FB_XMLCREF which was called 15 times, avg 1µs/call: # 15 times (22µs+0s) by Plack::Component::__ANON__[(eval 161)[/usr/share/perl5/Text/MicroTemplate.pm:389]:72] at line 64, avg 1µs/call sub Encode::FB_XMLCREF; # xsub
			# spent 7µs within Encode::PERLQQ which was called 2 times, avg 3µs/call: # once (6µs+0s) by XSLoader::load at line 92 of XSLoader.pm # once (700ns+0s) by PerlIO::import at line 16 of PerlIO/encoding.pm sub Encode::PERLQQ; # xsub
			# spent 500ns within Encode::STOP_AT_PARTIAL which was called: # once (500ns+0s) by PerlIO::import at line 16 of PerlIO/encoding.pm sub Encode::STOP_AT_PARTIAL; # xsub
			# spent 500ns within Encode::WARN_ON_ERR which was called: # once (500ns+0s) by PerlIO::import at line 16 of PerlIO/encoding.pm sub Encode::WARN_ON_ERR; # xsub
			# spent 101µs within Encode::is_utf8 which was called 40 times, avg 3µs/call: # 40 times (101µs+0s) by Template::Provider::_decode_unicode at line 1092 of Template/Provider.pm, avg 3µs/call sub Encode::is_utf8; # xsub
			# spent 54µs within Encode::utf8::encode_xs which was called: # once (54µs+0s) by CGI::Emulate::PSGI::__ANON__ at line 32 of CGI/Emulate/PSGI.pm sub Encode::utf8::encode_xs; # xsub
			# spent 3.99ms within File::Spec::Unix::canonpath which was called 965 times, avg 4µs/call: # 517 times (3.64ms+0s) by File::Spec::Unix::abs2rel at line 266 of File/Spec/Unix.pm, avg 7µs/call # 174 times (150µs+0s) by File::Spec::Unix::abs2rel at line 225 of File/Spec/Unix.pm, avg 861ns/call # 174 times (106µs+0s) by File::Spec::Unix::abs2rel at line 226 of File/Spec/Unix.pm, avg 612ns/call # 72 times (76µs+0s) by File::Spec::Unix::catdir or File::Spec::Unix::catfile at line 525 of Template/Provider.pm, avg 1µs/call # 24 times (12µs+0s) by File::Spec::Unix::catdir at line 190 of Module/Find.pm, avg 496ns/call # 2 times (3µs+0s) by File::Spec::Unix::catdir or File::Spec::Unix::catfile at line 26 of DateTime/TimeZone/Local/Unix.pm, avg 1µs/call # 2 times (2µs+0s) by File::Spec::Unix::catdir at line 183 of Module/Find.pm, avg 1µs/call sub File::Spec::Unix::canonpath; # xsub
			# spent 274µs (234+39) within File::Spec::Unix::catdir which was called 63 times, avg 4µs/call: # 36 times (152µs+24µs) by File::Spec::Unix::catfile at line 525 of Template/Provider.pm, avg 5µs/call # 24 times (57µs+12µs) by Module::Find::_find at line 190 of Module/Find.pm, avg 3µs/call # 2 times (18µs+2µs) by Module::Find::_find at line 183 of Module/Find.pm, avg 10µs/call # once (6µs+900ns) by File::Spec::Unix::catfile at line 26 of DateTime/TimeZone/Local/Unix.pm sub File::Spec::Unix::catdir; # xsub
			# spent 628µs (391+237) within File::Spec::Unix::catfile which was called 37 times, avg 17µs/call: # 36 times (373µs+228µs) by Template::Provider::_fetch_path at line 525 of Template/Provider.pm, avg 17µs/call # once (18µs+9µs) by DateTime::TimeZone::Local::Unix::_EtcFile at line 26 of DateTime/TimeZone/Local/Unix.pm sub File::Spec::Unix::catfile; # xsub
			# spent 1µs within Internals::SvREADONLY which was called: # once (1µs+0s) by Class::C3::Componentised::ensure_class_loaded at line 1848 of DBIx/Class/ResultSource.pm sub Internals::SvREADONLY; # xsub
			# spent 58µs within List::MoreUtils::uniq which was called 8 times, avg 7µs/call: # 8 times (58µs+0s) by C4::Templates::themelanguage at line 258 of C4/Templates.pm, avg 7µs/call sub List::MoreUtils::uniq; # xsub
			# spent 56.3ms (52.0+4.29) within List::Util::first which was called 2714 times, avg 21µs/call: # 782 times (4.26ms+0s) by DBIx::Class::ResultSource::columns_info at line 472 of DBIx/Class/ResultSource.pm, avg 5µs/call # 320 times (32.9ms+2.17ms) by SQL::Abstract::_where_unary_op at line 637 of SQL/Abstract.pm, avg 110µs/call # 319 times (7.22ms+2.10ms) by SQL::Abstract::_where_hashpair_HASHREF at line 887 of SQL/Abstract.pm, avg 29µs/call # 319 times (916µs+0s) by DBIx::Class::ResultSet::_resolved_attrs at line 3524 of DBIx/Class/ResultSet.pm, avg 3µs/call # 319 times (727µs+0s) by DBIx::Class::ResultSet::search_rs at line 467 of DBIx/Class/ResultSet.pm, avg 2µs/call # 317 times (5.00ms+0s) by DBIx::Class::ResultSet::search_rs at line 491 of DBIx/Class/ResultSet.pm, avg 16µs/call # 317 times (872µs+0s) by DBIx::Class::Storage::DBI::_gen_sql_bind at line 1655 of DBIx/Class/Storage/DBI.pm, avg 3µs/call # 16 times (36µs+0s) by DBIx::Class::Componentised::inject_base at line 203 of Class/C3/Componentised.pm, avg 2µs/call # 2 times (35µs+16µs) by SQL::Abstract::_where_unary_op at line 635 of SQL/Abstract.pm, avg 25µs/call # 2 times (14µs+8µs) by SQL::Abstract::_where_HASHREF at line 601 of SQL/Abstract.pm, avg 11µs/call # once (2µs+0s) by DBIx::Class::ResultSetColumn::new at line 59 of DBIx/Class/ResultSetColumn.pm sub List::Util::first; # xsub
			# spent 30µs within POSIX::strftime which was called: # once (30µs+0s) by POSIX::strftime::Compiler::strftime at line 11 of (eval 1143)[POSIX/strftime/Compiler.pm:351] sub POSIX::strftime; # xsub
			# spent 80µs within Package::Stash::XS::name which was called 114 times, avg 702ns/call: # 29 times (26µs+0s) by Package::Stash::XS::namespace at line 381 of namespace/clean.pm, avg 903ns/call # 29 times (15µs+0s) by Package::Stash::XS::namespace at line 363 of namespace/clean.pm, avg 503ns/call # 28 times (25µs+0s) by Package::Stash::XS::namespace at line 213 of namespace/clean.pm, avg 904ns/call # 28 times (14µs+0s) by Package::Stash::XS::namespace at line 308 of namespace/clean.pm, avg 496ns/call sub Package::Stash::XS::name; # xsub
			# spent 1.65ms (1.57+80µs) within Package::Stash::XS::namespace which was called 1525 times, avg 1µs/call: # 704 times (391µs+0s) by B::Hooks::EndOfScope::XS::__ANON__ at line 237 of namespace/clean.pm, avg 555ns/call # 205 times (331µs+26µs) by namespace::clean::import at line 381 of namespace/clean.pm, avg 2µs/call # 176 times (412µs+25µs) by B::Hooks::EndOfScope::XS::__ANON__ at line 213 of namespace/clean.pm, avg 2µs/call # 176 times (161µs+14µs) by namespace::clean::import at line 308 of namespace/clean.pm, avg 995ns/call # 176 times (143µs+0s) by B::Hooks::EndOfScope::XS::__ANON__ at line 241 of namespace/clean.pm, avg 814ns/call # 58 times (122µs+15µs) by namespace::clean::import at line 363 of namespace/clean.pm, avg 2µs/call # 29 times (15µs+0s) by namespace::clean::import at line 365 of namespace/clean.pm, avg 510ns/call # once (500ns+0s) by B::Hooks::EndOfScope::XS::__ANON__ at line 250 of namespace/clean.pm sub Package::Stash::XS::namespace; # xsub
			# spent 56µs within Plack::Component::CORE:subst which was called 108 times, avg 519ns/call: # 45 times (22µs+0s) by Plack::Component::__ANON__[(eval 161)[/usr/share/perl5/Text/MicroTemplate.pm:389]:72] at line 34, avg 480ns/call # 15 times (11µs+0s) by Plack::Component::__ANON__[(eval 161)[/usr/share/perl5/Text/MicroTemplate.pm:389]:72] at line 56, avg 740ns/call # 15 times (5µs+0s) by Plack::Component::__ANON__[(eval 161)[/usr/share/perl5/Text/MicroTemplate.pm:389]:72] at line 59, avg 353ns/call # 15 times (5µs+0s) by Plack::Component::__ANON__[(eval 161)[/usr/share/perl5/Text/MicroTemplate.pm:389]:72] at line 38, avg 333ns/call # 9 times (4µs+0s) by Plack::Component::__ANON__[(eval 161)[/usr/share/perl5/Text/MicroTemplate.pm:389]:72] at line 40, avg 400ns/call # 3 times (8µs+0s) by Plack::Component::__ANON__[(eval 161)[/usr/share/perl5/Text/MicroTemplate.pm:389]:72] at line 11, avg 3µs/call # 3 times (800ns+0s) by Plack::Component::__ANON__[(eval 161)[/usr/share/perl5/Text/MicroTemplate.pm:389]:72] at line 15, avg 267ns/call # 3 times (500ns+0s) by Plack::Component::__ANON__[(eval 161)[/usr/share/perl5/Text/MicroTemplate.pm:389]:72] at line 21, avg 167ns/call sub Plack::Component::CORE:subst; # opcode
			# spent 2.45ms within Scalar::Util::blessed which was called 3218 times, avg 763ns/call: # 1287 times (754µs+0s) by SQL::Abstract::_refkind at line 1474 of SQL/Abstract.pm, avg 586ns/call # 991 times (623µs+0s) by DBIx::Class::AccessorGroup::get_component_class at line 16 of DBIx/Class/AccessorGroup.pm, avg 629ns/call # 317 times (300µs+0s) by DBIx::Class::Storage::DBI::_gen_sql_bind at line 1643 of DBIx/Class/Storage/DBI.pm, avg 947ns/call # 316 times (255µs+0s) by DBIx::Class::Storage::DBIHacks::_resolve_ident_sources at line 683 of DBIx/Class/Storage/DBIHacks.pm, avg 809ns/call # 174 times (295µs+0s) by DBIx::Class::ResultSourceProxy::Table::table at line 84 of DBIx/Class/ResultSourceProxy/Table.pm, avg 2µs/call # 44 times (44µs+0s) by Template::Context::template at line 87 of Template/Context.pm, avg 1µs/call # 40 times (118µs+0s) by Template::Context::process at line 331 of Template/Context.pm, avg 3µs/call # 40 times (56µs+0s) by Template::Context::process at line 373 of Template/Context.pm, avg 1µs/call # 4 times (4µs+0s) by Method::Generate::Accessor::_generate_call_code at line 459 of Method/Generate/Accessor.pm, avg 875ns/call # 4 times (3µs+0s) by Template::Context::process at line 339 of Template/Context.pm, avg 850ns/call # once (900ns+0s) by Template::Iterator::new at line 55 of Template/Iterator.pm sub Scalar::Util::blessed; # xsub
			# spent 4µs within Scalar::Util::refaddr which was called 3 times, avg 1µs/call: # 2 times (2µs+0s) by DBIx::Class::Storage::DBI::Cursor::new at line 70 of DBIx/Class/Storage/DBI/Cursor.pm, avg 1µs/call # once (1µs+0s) by DBIx::Class::Storage::DBI::_arm_global_destructor at line 221 of DBIx/Class/Storage/DBI.pm sub Scalar::Util::refaddr; # xsub
			# spent 4.15ms within Scalar::Util::reftype which was called 4339 times, avg 955ns/call: # 3206 times (2.96ms+0s) by Class::Accessor::Grouped::get_inherited at line 364 of Class/Accessor/Grouped.pm, avg 924ns/call # 318 times (361µs+0s) by DBIx::Class::Storage::BlockRunner::new at line 82 of (eval 1109)[Sub/Quote.pm:5], avg 1µs/call # 318 times (341µs+0s) by DBIx::Class::Storage::BlockRunner::run at line 112 of DBIx/Class/Storage/BlockRunner.pm, avg 1µs/call # 317 times (352µs+0s) by DBIx::Class::Storage::DBI::_select_args at line 2498 of DBIx/Class/Storage/DBI.pm, avg 1µs/call # 180 times (130µs+0s) by Class::Accessor::Grouped::set_inherited at line 410 of Class/Accessor/Grouped.pm, avg 722ns/call sub Scalar::Util::reftype; # xsub
			# spent 3.22ms within Scalar::Util::weaken which was called 3825 times, avg 841ns/call: # 541 times (543µs+0s) by Sub::Defer::defer_sub at line 59 of Sub/Defer.pm, avg 1µs/call # 541 times (256µs+0s) by Sub::Defer::defer_sub at line 60 of Sub/Defer.pm, avg 474ns/call # 539 times (557µs+0s) by Sub::Quote::quote_sub at line 102 of Sub/Quote.pm, avg 1µs/call # 539 times (349µs+0s) by Sub::Quote::quote_sub at line 103 of Sub/Quote.pm, avg 647ns/call # 539 times (258µs+0s) by Sub::Quote::quote_sub at line 104 of Sub/Quote.pm, avg 479ns/call # 318 times (516µs+0s) by DBIx::Class::Storage::BlockRunner::_run at line 132 of DBIx/Class/Storage/BlockRunner.pm, avg 2µs/call # 318 times (271µs+0s) by DBIx::Class::Storage::BlockRunner::_run at line 133 of DBIx/Class/Storage/BlockRunner.pm, avg 852ns/call # 177 times (177µs+0s) by DBIx::Class::AccessorGroup::get_component_class at line 25 of DBIx/Class/AccessorGroup.pm, avg 998ns/call # 174 times (153µs+0s) by DBIx::Class::Schema::_register_source at line 1357 of DBIx/Class/Schema.pm, avg 879ns/call # 90 times (69µs+0s) by Class::Accessor::Grouped::__ANON__[/usr/share/perl5/Class/Accessor/Grouped.pm:942] at line 916 of Class/Accessor/Grouped.pm, avg 766ns/call # 29 times (34µs+0s) by DBIx::Class::ResultSet::_result_class or DBIx::Class::ResultSet::result_source or DBIx::Class::ResultSource::_columns or DBIx::Class::ResultSource::_ordered_columns or DBIx::Class::ResultSource::_primaries or DBIx::Class::ResultSource::_relationships or DBIx::Class::ResultSource::_unique_constraints or DBIx::Class::ResultSource::name or DBIx::Class::ResultSource::source_name or DBIx::Class::Row::in_storage or DBIx::Class::SQLMaker::limit_dialect or DBIx::Class::SQLMaker::name_sep or DBIx::Class::Storage::DBI::Cursor::storage or DBIx::Class::Storage::DBI::_conn_pid or DBIx::Class::Storage::DBI::_connect_info or DBIx::Class::Storage::DBI::_dbh or DBIx::Class::Storage::DBI::_dbh_autocommit or DBIx::Class::Storage::DBI::_dbh_details or DBIx::Class::Storage::DBI::_dbic_connect_attributes or DBIx::Class::Storage::DBI::_driver_determined or DBIx::Class::Storage::DBI::_sql_maker or DBIx::Class::Storage::DBI::_sql_maker_opts or DBIx::Class::Storage::DBI::disable_sth_caching or DBIx::Class::Storage::DBI::on_connect_call or DBIx::Class::Storage::DBI::on_connect_do or DBIx::Class::Storage::DBI::unsafe or DBIx::Class::Storage::debug or DBIx::Class::Storage::schema or DBIx::Class::Storage::transaction_depth at line 906 of Class/Accessor/Grouped.pm, avg 1µs/call # 16 times (32µs+0s) by Sub::Quote::unquote_sub at line 163 of Sub/Quote.pm, avg 2µs/call # 2 times (2µs+0s) by DBIx::Class::Storage::DBI::Cursor::new at line 70 of DBIx/Class/Storage/DBI/Cursor.pm, avg 1µs/call # once (1µs+0s) by DBIx::Class::Storage::set_schema at line 75 of DBIx/Class/Storage.pm # once (800ns+0s) by DBIx::Class::Storage::DBI::_arm_global_destructor at line 221 of DBIx/Class/Storage/DBI.pm sub Scalar::Util::weaken; # xsub
			# spent 27.9ms within Sub::Name::subname which was called 4582 times, avg 6µs/call: # 3944 times (25.3ms+0s) by Class::Accessor::Grouped::_mk_group_accessors at line 151 of Class/Accessor/Grouped.pm, avg 6µs/call # 547 times (2.28ms+0s) by Moo::_Utils::_name_coderef at line 96 of Moo/_Utils.pm, avg 4µs/call # 29 times (109µs+0s) by DBIx::Class::ResultSet::_result_class or DBIx::Class::ResultSet::result_source or DBIx::Class::ResultSource::_columns or DBIx::Class::ResultSource::_ordered_columns or DBIx::Class::ResultSource::_primaries or DBIx::Class::ResultSource::_relationships or DBIx::Class::ResultSource::_unique_constraints or DBIx::Class::ResultSource::name or DBIx::Class::ResultSource::source_name or DBIx::Class::Row::in_storage or DBIx::Class::SQLMaker::limit_dialect or DBIx::Class::SQLMaker::name_sep or DBIx::Class::Storage::DBI::Cursor::storage or DBIx::Class::Storage::DBI::_conn_pid or DBIx::Class::Storage::DBI::_connect_info or DBIx::Class::Storage::DBI::_dbh or DBIx::Class::Storage::DBI::_dbh_autocommit or DBIx::Class::Storage::DBI::_dbh_details or DBIx::Class::Storage::DBI::_dbic_connect_attributes or DBIx::Class::Storage::DBI::_driver_determined or DBIx::Class::Storage::DBI::_sql_maker or DBIx::Class::Storage::DBI::_sql_maker_opts or DBIx::Class::Storage::DBI::disable_sth_caching or DBIx::Class::Storage::DBI::on_connect_call or DBIx::Class::Storage::DBI::on_connect_do or DBIx::Class::Storage::DBI::unsafe or DBIx::Class::Storage::debug or DBIx::Class::Storage::schema or DBIx::Class::Storage::transaction_depth at line 898 of Class/Accessor/Grouped.pm, avg 4µs/call # 12 times (61µs+0s) by DBIx::Class::Relationship::ManyToMany::many_to_many at line 70 of DBIx/Class/Relationship/ManyToMany.pm, avg 5µs/call # 12 times (47µs+0s) by DBIx::Class::Relationship::ManyToMany::many_to_many at line 78 of DBIx/Class/Relationship/ManyToMany.pm, avg 4µs/call # 12 times (47µs+0s) by DBIx::Class::Relationship::ManyToMany::many_to_many at line 127 of DBIx/Class/Relationship/ManyToMany.pm, avg 4µs/call # 12 times (46µs+0s) by DBIx::Class::Relationship::ManyToMany::many_to_many at line 109 of DBIx/Class/Relationship/ManyToMany.pm, avg 4µs/call # 12 times (42µs+0s) by DBIx::Class::Relationship::ManyToMany::many_to_many at line 146 of DBIx/Class/Relationship/ManyToMany.pm, avg 3µs/call # once (6µs+0s) by DBIx::Class::SQLMaker::BEGIN@67 at line 75 of DBIx/Class/SQLMaker.pm # once (4µs+0s) by DBIx::Class::SQLMaker::BEGIN@67 at line 80 of DBIx/Class/SQLMaker.pm sub Sub::Name::subname; # xsub
			# spent 52µs within Tie::Hash::NamedCapture::FETCH which was called 12 times, avg 4µs/call: # 12 times (52µs+0s) by C4::NewsChannels::GetNewsToDisplay at line 133 of Koha/DateUtils.pm, avg 4µs/call sub Tie::Hash::NamedCapture::FETCH; # xsub
			# spent 17.2ms within UNIVERSAL::can which was called 3453 times, avg 5µs/call: # 1922 times (9.25ms+0s) by Class::Accessor::Grouped::_mk_group_accessors at line 91 of Class/Accessor/Grouped.pm, avg 5µs/call # 641 times (1.19ms+0s) by SQL::Abstract::_METHOD_FOR_refkind at line 1501 of SQL/Abstract.pm, avg 2µs/call # 315 times (2.73ms+0s) by DBIx::Class::ResultSet::_construct_results at line 1369 of DBIx/Class/ResultSet.pm, avg 9µs/call # 174 times (2.46ms+0s) by DBIx::Class::ResultSourceProxy::Table::table at line 91 of DBIx/Class/ResultSourceProxy/Table.pm, avg 14µs/call # 174 times (343µs+0s) by DBIx::Class::ResultSourceProxy::Table::table at line 99 of DBIx/Class/ResultSourceProxy/Table.pm, avg 2µs/call # 58 times (214µs+0s) by DBIx::Class::ResultSet::_result_class or DBIx::Class::ResultSet::result_source or DBIx::Class::ResultSource::_columns or DBIx::Class::ResultSource::_ordered_columns or DBIx::Class::ResultSource::_primaries or DBIx::Class::ResultSource::_relationships or DBIx::Class::ResultSource::_unique_constraints or DBIx::Class::ResultSource::name or DBIx::Class::ResultSource::source_name or DBIx::Class::Row::in_storage or DBIx::Class::SQLMaker::limit_dialect or DBIx::Class::SQLMaker::name_sep or DBIx::Class::Storage::DBI::Cursor::storage or DBIx::Class::Storage::DBI::_conn_pid or DBIx::Class::Storage::DBI::_connect_info or DBIx::Class::Storage::DBI::_dbh or DBIx::Class::Storage::DBI::_dbh_autocommit or DBIx::Class::Storage::DBI::_dbh_details or DBIx::Class::Storage::DBI::_dbic_connect_attributes or DBIx::Class::Storage::DBI::_driver_determined or DBIx::Class::Storage::DBI::_sql_maker or DBIx::Class::Storage::DBI::_sql_maker_opts or DBIx::Class::Storage::DBI::disable_sth_caching or DBIx::Class::Storage::DBI::on_connect_call or DBIx::Class::Storage::DBI::on_connect_do or DBIx::Class::Storage::DBI::unsafe or DBIx::Class::Storage::debug or DBIx::Class::Storage::schema or DBIx::Class::Storage::transaction_depth at line 815 of Class/Accessor/Grouped.pm, avg 4µs/call # 48 times (667µs+0s) by DBIx::Class::Relationship::ManyToMany::many_to_many at line 39 of DBIx/Class/Relationship/ManyToMany.pm, avg 14µs/call # 29 times (48µs+0s) by DBIx::Class::ResultSet::_result_class or DBIx::Class::ResultSet::result_source or DBIx::Class::ResultSource::_columns or DBIx::Class::ResultSource::_ordered_columns or DBIx::Class::ResultSource::_primaries or DBIx::Class::ResultSource::_relationships or DBIx::Class::ResultSource::_unique_constraints or DBIx::Class::ResultSource::name or DBIx::Class::ResultSource::source_name or DBIx::Class::Row::in_storage or DBIx::Class::SQLMaker::limit_dialect or DBIx::Class::SQLMaker::name_sep or DBIx::Class::Storage::DBI::Cursor::storage or DBIx::Class::Storage::DBI::_conn_pid or DBIx::Class::Storage::DBI::_connect_info or DBIx::Class::Storage::DBI::_dbh or DBIx::Class::Storage::DBI::_dbh_autocommit or DBIx::Class::Storage::DBI::_dbh_details or DBIx::Class::Storage::DBI::_dbic_connect_attributes or DBIx::Class::Storage::DBI::_driver_determined or DBIx::Class::Storage::DBI::_sql_maker or DBIx::Class::Storage::DBI::_sql_maker_opts or DBIx::Class::Storage::DBI::disable_sth_caching or DBIx::Class::Storage::DBI::on_connect_call or DBIx::Class::Storage::DBI::on_connect_do or DBIx::Class::Storage::DBI::unsafe or DBIx::Class::Storage::debug or DBIx::Class::Storage::schema or DBIx::Class::Storage::transaction_depth at line 860 of Class/Accessor/Grouped.pm, avg 2µs/call # 29 times (45µs+0s) by DBIx::Class::ResultSet::_result_class or DBIx::Class::ResultSet::result_source or DBIx::Class::ResultSource::_columns or DBIx::Class::ResultSource::_ordered_columns or DBIx::Class::ResultSource::_primaries or DBIx::Class::ResultSource::_relationships or DBIx::Class::ResultSource::_unique_constraints or DBIx::Class::ResultSource::name or DBIx::Class::ResultSource::source_name or DBIx::Class::Row::in_storage or DBIx::Class::SQLMaker::limit_dialect or DBIx::Class::SQLMaker::name_sep or DBIx::Class::Storage::DBI::Cursor::storage or DBIx::Class::Storage::DBI::_conn_pid or DBIx::Class::Storage::DBI::_connect_info or DBIx::Class::Storage::DBI::_dbh or DBIx::Class::Storage::DBI::_dbh_autocommit or DBIx::Class::Storage::DBI::_dbh_details or DBIx::Class::Storage::DBI::_dbic_connect_attributes or DBIx::Class::Storage::DBI::_driver_determined or DBIx::Class::Storage::DBI::_sql_maker or DBIx::Class::Storage::DBI::_sql_maker_opts or DBIx::Class::Storage::DBI::disable_sth_caching or DBIx::Class::Storage::DBI::on_connect_call or DBIx::Class::Storage::DBI::on_connect_do or DBIx::Class::Storage::DBI::unsafe or DBIx::Class::Storage::debug or DBIx::Class::Storage::schema or DBIx::Class::Storage::transaction_depth at line 837 of Class/Accessor/Grouped.pm, avg 2µs/call # 18 times (43µs+0s) by Class::C3::Componentised::ensure_class_loaded at line 119 of DBIx/Class/Storage/DBI.pm, avg 2µs/call # 9 times (46µs+0s) by CGI::Session::Serialize::yaml::thaw at line 24 of CGI/Session/Serialize/yaml.pm, avg 5µs/call # 9 times (36µs+0s) by CGI::Session::Serialize::yaml::freeze at line 18 of CGI/Session/Serialize/yaml.pm, avg 4µs/call # 4 times (9µs+0s) by Method::Generate::Accessor::_generate_xs at line 646 of Method/Generate/Accessor.pm, avg 2µs/call # 2 times (10µs+0s) by Method::Generate::Constructor::generate_method at line 103 of Method/Generate/Constructor.pm, avg 5µs/call # 2 times (9µs+0s) by Method::Generate::Constructor::generate_method at line 94 of Method/Generate/Constructor.pm, avg 4µs/call # 2 times (6µs+0s) by Method::Generate::Constructor::generate_method at line 109 of Method/Generate/Constructor.pm, avg 3µs/call # 2 times (5µs+0s) by Method::Generate::Constructor::new or Moo::Object::new at line 13 of Moo/Object.pm, avg 3µs/call # 2 times (5µs+0s) by Method::Generate::Constructor::new or Moo::Object::new at line 22 of Moo/Object.pm, avg 2µs/call # 2 times (4µs+0s) by Moo::_constructor_maker_for at line 155 of Moo.pm, avg 2µs/call # 2 times (3µs+0s) by Moo::_accessor_maker_for at line 128 of Moo.pm, avg 1µs/call # 2 times (2µs+0s) by Moo::_constructor_maker_for at line 157 of Moo.pm, avg 1µs/call # once (21µs+0s) by DBIx::Class::SQLMaker::select at line 146 of DBIx/Class/SQLMaker.pm # once (10µs+0s) by attributes::import at line 59 of attributes.pm # once (7µs+0s) by DBIx::Class::Storage::DBI::_determine_driver at line 1288 of DBIx/Class/Storage/DBI.pm # once (4µs+0s) by Moo::__ANON__[/usr/share/perl5/Moo.pm:183] at line 179 of Moo.pm # once (4µs+0s) by DBIx::Class::SQLMaker::select at line 160 of DBIx/Class/SQLMaker.pm # once (2µs+0s) by base::import at line 780 of Class/Accessor/Grouped.pm # once (1µs+0s) by base::import at line 781 of Class/Accessor/Grouped.pm sub UNIVERSAL::can; # xsub
			# spent 2.86ms within UNIVERSAL::isa which was called 779 times, avg 4µs/call: # 637 times (2.64ms+0s) by DBIx::Class::ResultSet::new at line 310 of DBIx/Class/ResultSet.pm, avg 4µs/call # 36 times (70µs+0s) by Template::Context::process at line 331 of Template/Context.pm, avg 2µs/call # 36 times (30µs+0s) by Template::Context::process at line 373 of Template/Context.pm, avg 822ns/call # 32 times (50µs+0s) by DBIx::Class::Componentised::inject_base at line 38 of DBIx/Class/Componentised.pm, avg 2µs/call # 16 times (35µs+0s) by DBIx::Class::Componentised::inject_base at line 201 of Class/C3/Componentised.pm, avg 2µs/call # 8 times (18µs+0s) by DBIx::Class::Componentised::inject_base at line 20 of DBIx/Class/Componentised.pm, avg 2µs/call # 5 times (7µs+0s) by C4::Output::output_with_http_headers or CGI::header at line 17 of (eval 1139)[CGI.pm:932], avg 1µs/call # 4 times (10µs+0s) by Template::Context::template at line 87 of Template/Context.pm, avg 2µs/call # 4 times (2µs+0s) by Template::Context::process at line 339 of Template/Context.pm, avg 550ns/call # once (1µs+0s) by Template::Document::__ANON__[/home/vagrant/kohaclone/koha-tmpl/intranet-tmpl/prog/en/modules/intranet-main.tt:203] at line 192 of koha-tmpl/intranet-tmpl/prog/en/modules/intranet-main.tt sub UNIVERSAL::isa; # xsub
			# spent 1.85ms within mro::get_linear_isa which was called 688 times, avg 3µs/call: # 498 times (1.64ms+0s) by Class::Accessor::Grouped::get_super_paths at line 507 of Class/Accessor/Grouped.pm, avg 3µs/call # 174 times (192µs+0s) by DBIx::Class::Schema::CORE:sort at line 244 of DBIx/Class/Schema.pm, avg 1µs/call # 16 times (22µs+0s) by DBIx::Class::Componentised::inject_base at line 203 of Class/C3/Componentised.pm, avg 1µs/call sub mro::get_linear_isa; # xsub
			# spent 15µs within mro::set_mro which was called 5 times, avg 3µs/call: # 4 times (11µs+0s) by DBIx::Class::Componentised::inject_base at line 194 of Class/C3/Componentised.pm, avg 3µs/call # once (4µs+0s) by DBIx::Class::Storage::DBI::_determine_driver at line 1265 of DBIx/Class/Storage/DBI.pm sub mro::set_mro; # xsub
			# spent 164µs within version::vxs::_VERSION which was called 16 times, avg 10µs/call: # 10 times (109µs+0s) by strictures::VERSION at line 22 of strictures.pm, avg 11µs/call # once (16µs+0s) by DateTime::TimeZone::Local::Unix::BEGIN@6 at line 6 of DateTime/TimeZone/Local/Unix.pm # once (14µs+0s) by JSON::BEGIN@2 at line 2 of (eval 166)[JSON.pm:252] # once (8µs+0s) by Class::Accessor::Grouped::BEGIN@31 at line 50 of Class/Accessor/Grouped.pm # once (8µs+0s) by Method::Generate::Accessor::BEGIN@11 at line 17 of Method/Generate/Accessor.pm # once (4µs+0s) by Class::Accessor::Grouped::BEGIN@31 at line 51 of Class/Accessor/Grouped.pm # once (4µs+0s) by Method::Generate::Accessor::BEGIN@11 at line 21 of Method/Generate/Accessor.pm sub version::vxs::_VERSION; # xsub